[INFO] cloning repository https://github.com/randoguyname/bitstream-autocorrelation
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/randoguyname/bitstream-autocorrelation" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frandoguyname%2Fbitstream-autocorrelation", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frandoguyname%2Fbitstream-autocorrelation'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] d64867144507333f08ff0fe0970850b5c0197f7f
[INFO] testing randoguyname/bitstream-autocorrelation against try#28f95933dc0727396c07b48d0a8cb5211b7fb472 for pr-154065-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Frandoguyname%2Fbitstream-autocorrelation" "/workspace/builds/worker-4-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/randoguyname/bitstream-autocorrelation
[INFO] finished tweaking git repo https://github.com/randoguyname/bitstream-autocorrelation
[INFO] tweaked toml for git repo https://github.com/randoguyname/bitstream-autocorrelation written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/randoguyname/bitstream-autocorrelation on toolchain 28f95933dc0727396c07b48d0a8cb5211b7fb472
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/randoguyname/bitstream-autocorrelation already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 6b2043cc6421224d79e0563ac87d1037daffe398f971247fe54e2f151f0ceff4
[INFO] running `Command { std: "docker" "start" "-a" "6b2043cc6421224d79e0563ac87d1037daffe398f971247fe54e2f151f0ceff4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6b2043cc6421224d79e0563ac87d1037daffe398f971247fe54e2f151f0ceff4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6b2043cc6421224d79e0563ac87d1037daffe398f971247fe54e2f151f0ceff4", kill_on_drop: false }`
[INFO] [stdout] 6b2043cc6421224d79e0563ac87d1037daffe398f971247fe54e2f151f0ceff4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ad5c4ffe7965cc3a619077b5e3d6e53affa868c3cdbe6cabe26b67bb0aae84f8
[INFO] running `Command { std: "docker" "start" "-a" "ad5c4ffe7965cc3a619077b5e3d6e53affa868c3cdbe6cabe26b67bb0aae84f8", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling ryu v1.0.23
[INFO] [stderr]    Compiling itoa v1.0.17
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling csv-core v0.1.13
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling syn v2.0.116
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling bitstream-autocorrelation v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 8.62s
[INFO] running `Command { std: "docker" "inspect" "ad5c4ffe7965cc3a619077b5e3d6e53affa868c3cdbe6cabe26b67bb0aae84f8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ad5c4ffe7965cc3a619077b5e3d6e53affa868c3cdbe6cabe26b67bb0aae84f8", kill_on_drop: false }`
[INFO] [stdout] ad5c4ffe7965cc3a619077b5e3d6e53affa868c3cdbe6cabe26b67bb0aae84f8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ebd142c8c5fb10e1f3a048268401942594f7f0b15e5832246e8600aa1a0f8d11
[INFO] running `Command { std: "docker" "start" "-a" "ebd142c8c5fb10e1f3a048268401942594f7f0b15e5832246e8600aa1a0f8d11", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]    Compiling find-msvc-tools v0.1.9
[INFO] [stderr]    Compiling alsa-sys v0.3.1
[INFO] [stderr]    Compiling tinyvec_macros v0.1.1
[INFO] [stderr]    Compiling ogg v0.8.0
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling cpal v0.17.1
[INFO] [stderr]    Compiling hound v3.5.1
[INFO] [stderr]    Compiling claxon v0.4.3
[INFO] [stderr]    Compiling bytes v1.11.1
[INFO] [stderr]    Compiling syn v2.0.116
[INFO] [stderr]    Compiling tinyvec v1.10.0
[INFO] [stderr]    Compiling dasp_sample v0.11.0
[INFO] [stderr]    Compiling cc v1.2.56
[INFO] [stderr]    Compiling lewton v0.10.2
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling slice-ring-buffer v0.3.4
[INFO] [stderr]    Compiling socket2 v0.6.2
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling minimp3-sys v0.3.2
[INFO] [stderr]    Compiling alsa v0.10.0
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling bitstream-autocorrelation v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling minimp3 v0.5.2
[INFO] [stderr]    Compiling creak v0.3.0
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 18.44s
[INFO] running `Command { std: "docker" "inspect" "ebd142c8c5fb10e1f3a048268401942594f7f0b15e5832246e8600aa1a0f8d11", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ebd142c8c5fb10e1f3a048268401942594f7f0b15e5832246e8600aa1a0f8d11", kill_on_drop: false }`
[INFO] [stdout] ebd142c8c5fb10e1f3a048268401942594f7f0b15e5832246e8600aa1a0f8d11
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 39fb6e9a9a56e6c3d2ea1df9b56e80316d8688b7538996a8cc4595e8c89ed3bb
[INFO] running `Command { std: "docker" "start" "-a" "39fb6e9a9a56e6c3d2ea1df9b56e80316d8688b7538996a8cc4595e8c89ed3bb", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.15s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/bitstream_autocorrelation-ab3726960a4f26b0)
[INFO] [stdout] running 3 tests
[INFO] [stdout] [2m2026-06-13T09:50:57.409432Z[0m [32m INFO[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m test-files/test-246-guitar.mp3 has sample rate 44100
[INFO] [stdout] [2m2026-06-13T09:50:57.417170Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.418148Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 538 is a subharmonic of 80 (0.6435547 vs 0.64160156)
[INFO] [stdout] [2m2026-06-13T09:50:57.418720Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 76.89746 at 44100hZ = 573.49097hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.423847Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.424143Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.424681Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 93 with 182 (0.0703125 vs 0.9453125)
[INFO] [stdout] [2m2026-06-13T09:50:57.424826Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 182 with 355 (0.9453125 vs 0.9921875)
[INFO] [stdout] [2m2026-06-13T09:50:57.425615Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 355.13217 at 44100hZ = 124.179115hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.431825Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-06-13T09:50:57.431958Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 124.179115
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.432615Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 85 with 176 (0.05078125 vs 0.9667969)
[INFO] [stderr] ALSA lib confmisc.c:855:(parse_card) cannot find card '0'
[INFO] [stderr] ALSA lib conf.c:5204:(_snd_config_evaluate) function snd_func_card_inum returned error: No such file or directory
[INFO] [stderr] ALSA lib confmisc.c:422:(snd_func_concat) error evaluating strings
[INFO] [stderr] ALSA lib conf.c:5204:(_snd_config_evaluate) function snd_func_concat returned error: No such file or directory
[INFO] [stderr] ALSA lib confmisc.c:1342:(snd_func_refer) error evaluating name
[INFO] [stderr] ALSA lib conf.c:5204:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory
[INFO] [stderr] ALSA lib conf.c:5727:(snd_config_expand) Evaluate error: No such file or directory
[INFO] [stderr] ALSA lib pcm.c:2721:(snd_pcm_open_noupdate) Unknown PCM default
[INFO] [stdout] [2m2026-06-13T09:50:57.439830Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 176 with 357 (0.9667969 vs 0.99121094)
[INFO] [stdout] [2m2026-06-13T09:50:57.440014Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 715 is a subharmonic of 357 (0.99316406 vs 0.99121094)
[INFO] [stdout] [2m2026-06-13T09:50:57.440762Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 357.63272 at 44100hZ = 123.31087hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.446822Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-06-13T09:50:57.446914Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 123.31087
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.447262Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 178 (0.98828125 vs 0.9824219)
[INFO] [stdout] [2m2026-06-13T09:50:57.451820Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 714 is a subharmonic of 178 (0.9892578 vs 0.98828125)
[INFO] [stdout] [2m2026-06-13T09:50:57.451920Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 178 (0.9902344 vs 0.9892578)
[INFO] [stdout] [2m2026-06-13T09:50:57.452561Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.57811 at 44100hZ = 246.95076hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.452754Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (2)
[INFO] [stdout] [2m2026-06-13T09:50:57.453102Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9902344
[INFO] [stdout] [2m2026-06-13T09:50:57.453163Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [124.179115, 123.31087, 246.95076]
[INFO] [stdout] [2m2026-06-13T09:50:57.453204Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stdout] [2m2026-06-13T09:50:57.453279Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 124.179115
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.453720Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 221 is a subharmonic of 43 (0.50390625 vs 0.49609375)
[INFO] [stdout] [2m2026-06-13T09:50:57.456821Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 577 is a subharmonic of 43 (0.52441406 vs 0.50390625)
[INFO] [stdout] [2m2026-06-13T09:50:57.456910Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 934 is a subharmonic of 43 (0.53808594 vs 0.52441406)
[INFO] [stdout] [2m2026-06-13T09:50:57.456957Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 43 with 178 (0.53808594 vs 0.9892578)
[INFO] [stdout] [2m2026-06-13T09:50:57.462814Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 178 (0.99316406 vs 0.9892578)
[INFO] [stdout] [2m2026-06-13T09:50:57.463339Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.53876 at 44100hZ = 247.00519hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.463354Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (3)
[INFO] [stdout] [2m2026-06-13T09:50:57.463366Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.99316406
[INFO] [stdout] [2m2026-06-13T09:50:57.463377Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [247.00519, 123.31087, 246.95076]
[INFO] [stdout] [2m2026-06-13T09:50:57.463391Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 3
[INFO] [stdout] [2m2026-06-13T09:50:57.463404Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.95076
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.463805Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 51 with 138 (0.40722656 vs 0.5644531)
[INFO] [stdout] [2m2026-06-13T09:50:57.463828Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 179 (0.99121094 vs 0.98535156)
[INFO] [stdout] [2m2026-06-13T09:50:57.464436Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.62439 at 44100hZ = 246.88678hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.464451Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [247.00519, 246.88678, 246.95076]
[INFO] [stdout] [2m2026-06-13T09:50:57.464464Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 4
[INFO] [stdout] [2m2026-06-13T09:50:57.464476Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.95076
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.476198Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 52 with 150 (0.4140625 vs 0.6845703)
[INFO] [stdout] test tests::test_from_files ... FAILED
[INFO] [stdout] [2m2026-06-13T09:50:57.481979Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 181 (0.9873047 vs 0.98046875)
[INFO] [stdout] [2m2026-06-13T09:50:57.482582Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.00691 at 44100hZ = 246.3592hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.482600Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [247.00519, 246.88678, 246.3592]
[INFO] [stdout] [2m2026-06-13T09:50:57.482615Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 5
[INFO] [stdout] [2m2026-06-13T09:50:57.482628Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.88678
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.482900Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 70 with 149 (0.19726563 vs 0.6816406)
[INFO] [stdout] [2m2026-06-13T09:50:57.483589Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.07858 at 44100hZ = 246.2606hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.483609Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.2606, 246.88678, 246.3592]
[INFO] [stdout] [2m2026-06-13T09:50:57.483620Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 6
[INFO] [stdout] [2m2026-06-13T09:50:57.483631Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3592
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.483996Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 351 is a subharmonic of 171 (0.9394531 vs 0.92285156)
[INFO] [stdout] [2m2026-06-13T09:50:57.484017Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 171 with 179 (0.9394531 vs 0.9873047)
[INFO] [stdout] [2m2026-06-13T09:50:57.484301Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.34215 at 44100hZ = 247.2775hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.484313Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.2606, 247.2775, 246.3592]
[INFO] [stdout] [2m2026-06-13T09:50:57.484325Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 7
[INFO] [stdout] [2m2026-06-13T09:50:57.484334Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3592
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.484724Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 92 with 343 (0.13378906 vs 0.84472656)
[INFO] [stdout] [2m2026-06-13T09:50:57.484758Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 174 with 357 (0.95214844 vs 0.98339844)
[INFO] [stdout] [2m2026-06-13T09:50:57.487152Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 177.46011 at 44100hZ = 248.50655hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.487231Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.2606, 247.2775, 248.50655]
[INFO] [stdout] [2m2026-06-13T09:50:57.487266Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 8
[INFO] [stdout] [2m2026-06-13T09:50:57.487324Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 247.2775
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.487953Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 176 (0.9794922 vs 0.9609375)
[INFO] [stdout] [2m2026-06-13T09:50:57.490814Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 176 (0.984375 vs 0.9794922)
[INFO] [stdout] [2m2026-06-13T09:50:57.490893Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 176 (0.9863281 vs 0.984375)
[INFO] [stdout] [2m2026-06-13T09:50:57.490927Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 359 is a subharmonic of 176 (0.99121094 vs 0.9863281)
[INFO] [stdout] [2m2026-06-13T09:50:57.491475Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.48502 at 44100hZ = 245.70296hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.491542Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.70296, 247.2775, 248.50655]
[INFO] [stdout] [2m2026-06-13T09:50:57.491574Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 9
[INFO] [stdout] [2m2026-06-13T09:50:57.491626Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 247.2775
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.492642Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.40694 at 44100hZ = 245.80989hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.494808Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.70296, 245.80989, 248.50655]
[INFO] [stdout] [2m2026-06-13T09:50:57.494877Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 10
[INFO] [stdout] [2m2026-06-13T09:50:57.494912Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.80989
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.495245Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 84 with 181 (0.12402344 vs 0.9404297)
[INFO] [stdout] [2m2026-06-13T09:50:57.498354Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.7008 at 44100hZ = 246.7812hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.498437Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.70296, 245.80989, 246.7812]
[INFO] [stdout] [2m2026-06-13T09:50:57.498475Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 11
[INFO] [stdout] [2m2026-06-13T09:50:57.498542Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.80989
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.499007Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 100 with 209 (0.2763672 vs 0.6455078)
[INFO] [stdout] [2m2026-06-13T09:50:57.499368Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.88342 at 44100hZ = 246.52927hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.499408Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.52927, 245.80989, 246.7812]
[INFO] [stdout] [2m2026-06-13T09:50:57.499434Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 12
[INFO] [stdout] [2m2026-06-13T09:50:57.499457Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.52927
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.499857Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 538 is a subharmonic of 178 (0.9824219 vs 0.9824219)
[INFO] [stdout] [2m2026-06-13T09:50:57.500048Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 178 (0.98339844 vs 0.9824219)
[INFO] [stdout] [2m2026-06-13T09:50:57.500516Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 180.69453 at 44100hZ = 244.05829hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.503812Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.52927, 244.05829, 246.7812]
[INFO] [stdout] [2m2026-06-13T09:50:57.503894Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 13
[INFO] [stdout] [2m2026-06-13T09:50:57.503929Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.52927
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.504517Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 179 (0.98046875 vs 0.98046875)
[INFO] [stdout] [2m2026-06-13T09:50:57.504874Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.33658 at 44100hZ = 245.90633hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.504924Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.52927, 244.05829, 245.90633]
[INFO] [stdout] [2m2026-06-13T09:50:57.504956Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 14
[INFO] [stdout] [2m2026-06-13T09:50:57.505003Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.90633
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.505313Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 536 is a subharmonic of 179 (0.99316406 vs 0.99121094)
[INFO] [stdout] [2m2026-06-13T09:50:57.505736Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.20088 at 44100hZ = 246.09254hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.505808Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.09254, 244.05829, 245.90633]
[INFO] [stdout] [2m2026-06-13T09:50:57.505848Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 15
[INFO] [stdout] [2m2026-06-13T09:50:57.505899Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.90633
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.506802Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.21141 at 44100hZ = 246.07808hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.508807Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.09254, 246.07808, 245.90633]
[INFO] [stdout] [2m2026-06-13T09:50:57.508878Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 16
[INFO] [stdout] [2m2026-06-13T09:50:57.508909Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.07808
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.512202Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 58 with 183 (0.39160156 vs 0.8769531)
[INFO] [stdout] [2m2026-06-13T09:50:57.512298Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 183 with 895 (0.8769531 vs 0.93847656)
[INFO] [stdout] [2m2026-06-13T09:50:57.513004Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 895.3624 at 44100hZ = 49.2538hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.513105Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.513183Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.09254, 246.07808, 246.269]
[INFO] [stdout] [2m2026-06-13T09:50:57.513263Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 17
[INFO] [stdout] [2m2026-06-13T09:50:57.513351Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.09254
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.513827Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 359 is a subharmonic of 177 (0.9404297 vs 0.9355469)
[INFO] [stdout] [2m2026-06-13T09:50:57.513903Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 181 is a subharmonic of 177 (0.94921875 vs 0.9404297)
[INFO] [stdout] [2m2026-06-13T09:50:57.514552Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.625 at 44100hZ = 245.51149hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.514638Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.51149, 246.07808, 246.269]
[INFO] [stdout] [2m2026-06-13T09:50:57.514688Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 18
[INFO] [stdout] [2m2026-06-13T09:50:57.514767Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.07808
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.515271Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 53 with 177 (0.34375 vs 0.921875)
[INFO] [stdout] [2m2026-06-13T09:50:57.515509Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 360 is a subharmonic of 177 (0.9277344 vs 0.921875)
[INFO] [stdout] [2m2026-06-13T09:50:57.515576Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 177 (0.9345703 vs 0.9277344)
[INFO] [stdout] [2m2026-06-13T09:50:57.515615Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 177 (0.94140625 vs 0.9345703)
[INFO] [stdout] [2m2026-06-13T09:50:57.516215Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.15118 at 44100hZ = 246.16081hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.519814Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.51149, 246.16081, 246.269]
[INFO] [stdout] [2m2026-06-13T09:50:57.519903Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 19
[INFO] [stdout] [2m2026-06-13T09:50:57.519943Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.16081
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.520347Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 362 is a subharmonic of 183 (0.9189453 vs 0.9160156)
[INFO] [stdout] [2m2026-06-13T09:50:57.520413Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 183 with 537 (0.9189453 vs 0.9501953)
[INFO] [stdout] [2m2026-06-13T09:50:57.521095Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.81647 at 44100hZ = 246.62158hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.521154Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.51149, 246.16081, 246.62158]
[INFO] [stdout] [2m2026-06-13T09:50:57.521189Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 20
[INFO] [stdout] [2m2026-06-13T09:50:57.521241Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.16081
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.521723Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 46 with 175 (0.29882813 vs 0.8466797)
[INFO] [stdout] [2m2026-06-13T09:50:57.521777Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 175 with 358 (0.8466797 vs 0.92285156)
[INFO] [stdout] [2m2026-06-13T09:50:57.521831Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 358 (0.9375 vs 0.92285156)
[INFO] [stdout] [2m2026-06-13T09:50:57.522556Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 358.0625 at 44100hZ = 123.16286hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.522617Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.522657Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.32571, 246.16081, 246.62158]
[INFO] [stdout] [2m2026-06-13T09:50:57.522724Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 21
[INFO] [stdout] [2m2026-06-13T09:50:57.522758Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.32571
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.523220Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 46 with 171 (0.27539063 vs 0.8095703)
[INFO] [stdout] [2m2026-06-13T09:50:57.523318Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 171 with 353 (0.8095703 vs 0.84375)
[INFO] [stdout] [2m2026-06-13T09:50:57.523351Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 353 with 717 (0.84375 vs 0.92089844)
[INFO] [stdout] [2m2026-06-13T09:50:57.524005Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 359.67178 at 44100hZ = 122.611786hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.524132Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.524170Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.32571, 245.22357, 246.62158]
[INFO] [stdout] [2m2026-06-13T09:50:57.524354Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 22
[INFO] [stdout] [2m2026-06-13T09:50:57.524772Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.32571
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.525505Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 100 with 636 (0.5751953 vs 0.6044922)
[INFO] [stdout] [2m2026-06-13T09:50:57.525575Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 715 is a subharmonic of 182 (0.93359375 vs 0.9326172)
[INFO] [stdout] [2m2026-06-13T09:50:57.525606Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 182 (0.9511719 vs 0.93359375)
[INFO] [stdout] [2m2026-06-13T09:50:57.526284Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.24347 at 44100hZ = 246.03407hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.526382Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.32571, 245.22357, 246.03407]
[INFO] [stdout] [2m2026-06-13T09:50:57.526574Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 23
[INFO] [stdout] [2m2026-06-13T09:50:57.526603Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.03407
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.526915Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 44 with 179 (0.19238281 vs 0.95214844)
[INFO] [stdout] [2m2026-06-13T09:50:57.527586Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.3195 at 44100hZ = 245.92975hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.527679Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.92975, 245.22357, 246.03407]
[INFO] [stdout] [2m2026-06-13T09:50:57.528032Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 24
[INFO] [stdout] [2m2026-06-13T09:50:57.528116Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.92975
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.529417Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 178 (0.94140625 vs 0.93847656)
[INFO] [stdout] [2m2026-06-13T09:50:57.529553Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 179 is a subharmonic of 178 (0.94140625 vs 0.94140625)
[INFO] [stdout] [2m2026-06-13T09:50:57.530259Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.0091 at 44100hZ = 246.3562hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.530400Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.92975, 246.3562, 246.03407]
[INFO] [stdout] [2m2026-06-13T09:50:57.530419Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 25
[INFO] [stdout] [2m2026-06-13T09:50:57.530429Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.03407
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.531100Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 45 with 141 (0.17578125 vs 0.20507813)
[INFO] [stdout] [2m2026-06-13T09:50:57.531126Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 141 with 278 (0.20507813 vs 0.7314453)
[INFO] [stdout] [2m2026-06-13T09:50:57.531141Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 714 is a subharmonic of 357 (0.9453125 vs 0.94140625)
[INFO] [stdout] [2m2026-06-13T09:50:57.531626Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 357.0802 at 44100hZ = 123.50167hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.531639Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.531648Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.92975, 246.3562, 247.00334]
[INFO] [stdout] [2m2026-06-13T09:50:57.531660Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 26
[INFO] [stdout] [2m2026-06-13T09:50:57.531669Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3562
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.532189Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 32 with 210 (0.29296875 vs 0.33398438)
[INFO] [stdout] [2m2026-06-13T09:50:57.532233Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 705 is a subharmonic of 346 (0.7246094 vs 0.70703125)
[INFO] [stdout] [2m2026-06-13T09:50:57.532310Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 719 is a subharmonic of 178 (0.9267578 vs 0.9238281)
[INFO] [stdout] [2m2026-06-13T09:50:57.532344Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 180 is a subharmonic of 178 (0.9355469 vs 0.9267578)
[INFO] [stdout] [2m2026-06-13T09:50:57.532878Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 180.71922 at 44100hZ = 244.02495hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.532936Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.02495, 246.3562, 247.00334]
[INFO] [stdout] [2m2026-06-13T09:50:57.532969Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 27
[INFO] [stdout] [2m2026-06-13T09:50:57.533029Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.3562
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.533529Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 39 with 82 (0.19921875 vs 0.7421875)
[INFO] [stdout] [2m2026-06-13T09:50:57.533592Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 268 is a subharmonic of 82 (0.75683594 vs 0.7421875)
[INFO] [stdout] [2m2026-06-13T09:50:57.533627Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 620 is a subharmonic of 82 (0.7685547 vs 0.75683594)
[INFO] [stdout] [2m2026-06-13T09:50:57.533679Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 801 is a subharmonic of 82 (0.79003906 vs 0.7685547)
[INFO] [stdout] [2m2026-06-13T09:50:57.533712Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 82 with 894 (0.79003906 vs 0.9082031)
[INFO] [stdout] [2m2026-06-13T09:50:57.534514Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 359.01334 at 44100hZ = 122.83666hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.534567Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.534600Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.02495, 245.67332, 247.00334]
[INFO] [stdout] [2m2026-06-13T09:50:57.534674Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 28
[INFO] [stdout] [2m2026-06-13T09:50:57.535049Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.67332
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.535447Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 48 with 145 (0.14550781 vs 0.23339844)
[INFO] [stdout] [2m2026-06-13T09:50:57.535577Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 361 is a subharmonic of 183 (0.92578125 vs 0.91503906)
[INFO] [stdout] [2m2026-06-13T09:50:57.535630Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 539 is a subharmonic of 183 (0.9433594 vs 0.92578125)
[INFO] [stdout] [2m2026-06-13T09:50:57.535718Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 717 is a subharmonic of 183 (0.9482422 vs 0.9433594)
[INFO] [stdout] [2m2026-06-13T09:50:57.536602Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.93088 at 44100hZ = 246.46388hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.536665Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.02495, 245.67332, 246.46388]
[INFO] [stdout] [2m2026-06-13T09:50:57.536700Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 29
[INFO] [stdout] [2m2026-06-13T09:50:57.536753Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.67332
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.539163Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 896.38196 at 44100hZ = 49.197777hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.539228Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.539244Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.98889, 245.67332, 246.46388]
[INFO] [stdout] [2m2026-06-13T09:50:57.539256Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 30
[INFO] [stdout] [2m2026-06-13T09:50:57.539266Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.98889
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.539619Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 42 with 91 (0.125 vs 0.85546875)
[INFO] [stdout] [2m2026-06-13T09:50:57.539636Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 91 with 179 (0.85546875 vs 0.9316406)
[INFO] [stdout] [2m2026-06-13T09:50:57.539656Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 898 is a subharmonic of 179 (0.9394531 vs 0.9316406)
[INFO] [stdout] [2m2026-06-13T09:50:57.540544Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.85263 at 44100hZ = 245.20074hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.540562Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.98889, 245.20074, 246.46388]
[INFO] [stdout] [2m2026-06-13T09:50:57.540574Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 31
[INFO] [stdout] [2m2026-06-13T09:50:57.540583Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.98889
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.541044Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 717 is a subharmonic of 182 (0.93847656 vs 0.9199219)
[INFO] [stdout] [2m2026-06-13T09:50:57.541129Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 359 is a subharmonic of 182 (0.93847656 vs 0.93847656)
[INFO] [stdout] [2m2026-06-13T09:50:57.541186Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 716 is a subharmonic of 182 (0.9394531 vs 0.93847656)
[INFO] [stdout] [2m2026-06-13T09:50:57.541307Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 182 (0.94140625 vs 0.9394531)
[INFO] [stdout] [2m2026-06-13T09:50:57.542134Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.6923 at 44100hZ = 245.41953hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.542187Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [245.98889, 245.20074, 245.41953]
[INFO] [stdout] [2m2026-06-13T09:50:57.542217Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 32
[INFO] [stdout] [2m2026-06-13T09:50:57.542244Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.41953
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.542542Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 98 with 183 (0.81152344 vs 0.89941406)
[INFO] [stdout] [2m2026-06-13T09:50:57.542702Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 183 with 716 (0.89941406 vs 0.92285156)
[INFO] [stdout] test tests::test_with_microphone ... FAILED
[INFO] [stdout] [2m2026-06-13T09:50:57.543579Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 895.5994 at 44100hZ = 49.240765hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.543621Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.543631Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.20383, 245.20074, 245.41953]
[INFO] [stdout] [2m2026-06-13T09:50:57.543642Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 33
[INFO] [stdout] [2m2026-06-13T09:50:57.543652Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.41953
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.544093Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 537 is a subharmonic of 181 (0.9199219 vs 0.9160156)
[INFO] [stdout] [2m2026-06-13T09:50:57.544117Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 895 is a subharmonic of 181 (0.921875 vs 0.9199219)
[INFO] [stdout] [2m2026-06-13T09:50:57.545028Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.46667 at 44100hZ = 245.72807hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.545056Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.20383, 245.72807, 245.41953]
[INFO] [stdout] [2m2026-06-13T09:50:57.545068Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 34
[INFO] [stdout] [2m2026-06-13T09:50:57.545078Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.72807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.545459Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 46 with 184 (0.1875 vs 0.8095703)
[INFO] [stdout] [2m2026-06-13T09:50:57.545481Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 536 is a subharmonic of 184 (0.81152344 vs 0.8095703)
[INFO] [stdout] [2m2026-06-13T09:50:57.545502Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 723 is a subharmonic of 179 (0.8408203 vs 0.83984375)
[INFO] [stdout] [2m2026-06-13T09:50:57.545522Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 898 is a subharmonic of 179 (0.8457031 vs 0.8408203)
[INFO] [stdout] [2m2026-06-13T09:50:57.545540Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 713 is a subharmonic of 179 (0.86621094 vs 0.8457031)
[INFO] [stdout] [2m2026-06-13T09:50:57.546276Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.55682 at 44100hZ = 246.9802hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.546302Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.20383, 245.72807, 246.9802]
[INFO] [stdout] [2m2026-06-13T09:50:57.546316Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 35
[INFO] [stdout] [2m2026-06-13T09:50:57.546326Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.20383
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.546666Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 40 with 92 (0.19433594 vs 0.8388672)
[INFO] [stdout] [2m2026-06-13T09:50:57.546680Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 173 is a subharmonic of 92 (0.85253906 vs 0.8388672)
[INFO] [stdout] [2m2026-06-13T09:50:57.546693Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 92 with 537 (0.85253906 vs 0.88964844)
[INFO] [stdout] [2m2026-06-13T09:50:57.546793Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 179 (0.91796875 vs 0.9169922)
[INFO] [stdout] [2m2026-06-13T09:50:57.547397Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 178.69363 at 44100hZ = 246.7911hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.547414Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.7911, 245.72807, 246.9802]
[INFO] [stdout] [2m2026-06-13T09:50:57.547426Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 36
[INFO] [stdout] [2m2026-06-13T09:50:57.547436Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.7911
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.547867Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 98 with 182 (0.7910156 vs 0.890625)
[INFO] [stdout] [2m2026-06-13T09:50:57.547893Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 541 is a subharmonic of 182 (0.89746094 vs 0.890625)
[INFO] [stdout] [2m2026-06-13T09:50:57.547931Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 894 is a subharmonic of 177 (0.9033203 vs 0.9033203)
[INFO] [stdout] [2m2026-06-13T09:50:57.547948Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 356 is a subharmonic of 177 (0.9169922 vs 0.9033203)
[INFO] [stdout] [2m2026-06-13T09:50:57.547964Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 897 is a subharmonic of 177 (0.9277344 vs 0.9169922)
[INFO] [stdout] [2m2026-06-13T09:50:57.548595Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.63394 at 44100hZ = 245.49927hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.548613Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.7911, 245.49927, 246.9802]
[INFO] [stdout] [2m2026-06-13T09:50:57.548625Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 37
[INFO] [stdout] [2m2026-06-13T09:50:57.548635Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.7911
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.549103Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 47 with 126 (0.14648438 vs 0.20898438)
[INFO] [stdout] [2m2026-06-13T09:50:57.549136Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 720 is a subharmonic of 182 (0.8847656 vs 0.8808594)
[INFO] [stdout] [2m2026-06-13T09:50:57.549166Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 357 is a subharmonic of 182 (0.89453125 vs 0.8847656)
[INFO] [stdout] [2m2026-06-13T09:50:57.549183Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 717 is a subharmonic of 182 (0.89941406 vs 0.89453125)
[INFO] [stdout] [2m2026-06-13T09:50:57.549605Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 179.28572 at 44100hZ = 245.97609hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.549620Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [246.7911, 245.49927, 245.97609]
[INFO] [stdout] [2m2026-06-13T09:50:57.549633Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 38
[INFO] [stdout] [2m2026-06-13T09:50:57.549644Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.97609
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.550080Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 354 is a subharmonic of 180 (0.86035156 vs 0.85546875)
[INFO] [stdout] [2m2026-06-13T09:50:57.550206Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 539 is a subharmonic of 180 (0.86816406 vs 0.86035156)
[INFO] [stdout] [2m2026-06-13T09:50:57.550221Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 902 is a subharmonic of 180 (0.8769531 vs 0.86816406)
[INFO] [stdout] [2m2026-06-13T09:50:57.550235Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 180 with 359 (0.8769531 vs 0.90722656)
[INFO] [stdout] [2m2026-06-13T09:50:57.550769Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 360.53333 at 44100hZ = 122.31879hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.550855Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.550868Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.63757, 245.49927, 245.97609]
[INFO] [stdout] [2m2026-06-13T09:50:57.550880Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 39
[INFO] [stdout] [2m2026-06-13T09:50:57.550890Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.49927
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.551266Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 187 with 365 (0.8144531 vs 0.8544922)
[INFO] [stdout] [2m2026-06-13T09:50:57.551291Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 178 with 359 (0.88964844 vs 0.91308594)
[INFO] [stdout] [2m2026-06-13T09:50:57.551868Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 895.1538 at 44100hZ = 49.265278hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.551889Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.551903Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.63757, 246.32639, 245.97609]
[INFO] [stdout] [2m2026-06-13T09:50:57.551936Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 40
[INFO] [stdout] [2m2026-06-13T09:50:57.551948Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.97609
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.552336Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 705 is a subharmonic of 76 (0.70410156 vs 0.6953125)
[INFO] [stdout] [2m2026-06-13T09:50:57.552356Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 76 with 445 (0.70410156 vs 0.8496094)
[INFO] [stdout] [2m2026-06-13T09:50:57.552967Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 717.7778 at 44100hZ = 61.43963hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.552990Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.553003Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.63757, 246.32639, 245.75851]
[INFO] [stdout] [2m2026-06-13T09:50:57.553016Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 41
[INFO] [stdout] [2m2026-06-13T09:50:57.553027Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.75851
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.553294Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 262 is a subharmonic of 81 (0.8105469 vs 0.8046875)
[INFO] [stdout] [2m2026-06-13T09:50:57.553307Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 718 is a subharmonic of 81 (0.8300781 vs 0.8105469)
[INFO] [stdout] [2m2026-06-13T09:50:57.553321Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 358 is a subharmonic of 181 (0.8925781 vs 0.88671875)
[INFO] [stdout] [2m2026-06-13T09:50:57.553972Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 180.30833 at 44100hZ = 244.58104hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.553995Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.58104, 246.32639, 245.75851]
[INFO] [stdout] [2m2026-06-13T09:50:57.554009Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 42
[INFO] [stdout] [2m2026-06-13T09:50:57.554021Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.75851
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.554501Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 52 with 354 (0.25683594 vs 0.8232422)
[INFO] [stdout] [2m2026-06-13T09:50:57.555219Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 356.06668 at 44100hZ = 123.8532hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.555275Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.555318Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.58104, 247.7064, 245.75851]
[INFO] [stdout] [2m2026-06-13T09:50:57.555393Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 43
[INFO] [stdout] [2m2026-06-13T09:50:57.555426Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.75851
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.555960Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 173 with 895 (0.81152344 vs 0.85546875)
[INFO] [stdout] [2m2026-06-13T09:50:57.556507Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 893.1944 at 44100hZ = 49.373352hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.556530Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.556541Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [244.58104, 247.7064, 246.86676]
[INFO] [stdout] [2m2026-06-13T09:50:57.556554Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 44
[INFO] [stdout] [2m2026-06-13T09:50:57.556565Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.86676
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.556970Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 91 with 538 (0.7529297 vs 0.8222656)
[INFO] [stdout] [2m2026-06-13T09:50:57.557595Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 544.89087 at 44100hZ = 80.93364hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.557609Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.557620Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [242.80092, 247.7064, 246.86676]
[INFO] [stdout] [2m2026-06-13T09:50:57.557632Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 45
[INFO] [stdout] [2m2026-06-13T09:50:57.557643Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 246.86676
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.558122Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 91 with 898 (0.7861328 vs 0.8574219)
[INFO] [stdout] [2m2026-06-13T09:50:57.558752Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 896.50793 at 44100hZ = 49.190865hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.558834Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Checking for harmonics & subharmonics
[INFO] [stdout] [2m2026-06-13T09:50:57.558868Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [242.80092, 245.95432, 246.86676]
[INFO] [stdout] [2m2026-06-13T09:50:57.558922Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 46
[INFO] [stdout] [2m2026-06-13T09:50:57.558968Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.95432
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.559951Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 81.94286 at 44100hZ = 538.1799hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.560012Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.560029Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.560425Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 136 with 539 (0.4560547 vs 0.57128906)
[INFO] [stdout] [2m2026-06-13T09:50:57.560449Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 97 with 719 (0.6591797 vs 0.7158203)
[INFO] [stdout] [2m2026-06-13T09:50:57.560895Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 894.1667 at 44100hZ = 49.319664hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.560913Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.560925Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.561413Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 358 with 711 (0.6484375 vs 0.6816406)
[INFO] [stdout] [2m2026-06-13T09:50:57.562179Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 89.9 at 44100hZ = 490.54504hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.562251Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.562291Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.562900Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 88 with 178 (0.7011719 vs 0.74121094)
[INFO] [stdout] [2m2026-06-13T09:50:57.563735Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 175.37143 at 44100hZ = 251.46628hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.563761Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [242.80092, 245.95432, 251.46628]
[INFO] [stdout] [2m2026-06-13T09:50:57.563774Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-06-13T09:50:57.563802Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 245.95432
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.565095Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 367.80002 at 44100hZ = 119.902115hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.565157Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.565192Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.565709Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 93 with 535 (0.51953125 vs 0.5966797)
[INFO] [stdout] [2m2026-06-13T09:50:57.566591Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 172.85713 at 44100hZ = 255.12398hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.566613Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.566625Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.567122Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m Replacing 147 with 451 (0.35351563 vs 0.47558594)
[INFO] [stdout] [2m2026-06-13T09:50:57.567729Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 736.7778 at 44100hZ = 59.855225hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.567746Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.567757Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.568859Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 437.5 at 44100hZ = 100.8hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.568920Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.568946Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Unconfident shift at 0.8388672
[INFO] [stdout] [2m2026-06-13T09:50:57.568959Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.570585Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 198.36363 at 44100hZ = 222.31898hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.570602Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.570613Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.572099Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 348.4 at 44100hZ = 126.57864hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.572160Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.572174Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.573232Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.573249Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.573260Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Unconfident shift at 0.80078125
[INFO] [stdout] [2m2026-06-13T09:50:57.573269Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.575278Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 16.5 at 44100hZ = 2672.7273hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.575341Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.575357Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Unconfident shift at 0.8125
[INFO] [stdout] [2m2026-06-13T09:50:57.575367Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.576981Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.577001Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.577012Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.90625
[INFO] [stdout] [2m2026-06-13T09:50:57.577022Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 245.95432, 251.46628]
[INFO] [stdout] [2m2026-06-13T09:50:57.577042Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-06-13T09:50:57.577054Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 251.46628
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.577495Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 871.0833 at 44100hZ = 50.626617hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.577513Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.577523Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.578482Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.578544Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.578576Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.579937Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.579998Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.580013Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-06-13T09:50:57.580023Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1422.5807, 251.46628]
[INFO] [stdout] [2m2026-06-13T09:50:57.580055Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift detected, reset frames from 0
[INFO] [stdout] [2m2026-06-13T09:50:57.580078Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.581707Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.581729Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1422.5807, 1422.5807]
[INFO] [stdout] [2m2026-06-13T09:50:57.581742Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-06-13T09:50:57.581751Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.582540Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 31 at 44100hZ = 1422.5807hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.582557Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1422.5807, 1422.5807]
[INFO] [stdout] [2m2026-06-13T09:50:57.582568Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-06-13T09:50:57.582578Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.584390Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.584457Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (2)
[INFO] [stdout] [2m2026-06-13T09:50:57.584476Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-06-13T09:50:57.584487Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1331.8793, 1422.5807]
[INFO] [stdout] [2m2026-06-13T09:50:57.584499Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stdout] [2m2026-06-13T09:50:57.584509Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1422.5807
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.587055Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.587121Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (3)
[INFO] [stdout] [2m2026-06-13T09:50:57.587157Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-06-13T09:50:57.587213Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1422.5807, 1331.8793, 1331.8793]
[INFO] [stdout] [2m2026-06-13T09:50:57.587250Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift detected, reset frames from 3
[INFO] [stdout] [2m2026-06-13T09:50:57.587302Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.589752Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.589834Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 1331.8793]
[INFO] [stdout] [2m2026-06-13T09:50:57.589877Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-06-13T09:50:57.589909Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.592214Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.592272Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 1331.8793]
[INFO] [stdout] [2m2026-06-13T09:50:57.592306Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-06-13T09:50:57.592355Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.594629Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 153 at 44100hZ = 288.2353hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.594714Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (2)
[INFO] [stdout] [2m2026-06-13T09:50:57.594754Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 1
[INFO] [stdout] [2m2026-06-13T09:50:57.594813Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 288.2353]
[INFO] [stdout] [2m2026-06-13T09:50:57.594847Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stdout] [2m2026-06-13T09:50:57.594915Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.595343Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.595812Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.596400Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m 844 is a subharmonic of 173 (0.8310547 vs 0.8310547)
[INFO] [stdout] [2m2026-06-13T09:50:57.598506Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.598580Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 288.2353]
[INFO] [stdout] [2m2026-06-13T09:50:57.598615Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-06-13T09:50:57.598664Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.599240Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.601609Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.601673Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 288.2353]
[INFO] [stdout] [2m2026-06-13T09:50:57.601690Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-06-13T09:50:57.601701Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.603531Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 926 at 44100hZ = 47.62419hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.603548Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (1)
[INFO] [stdout] [2m2026-06-13T09:50:57.603558Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9707031
[INFO] [stdout] [2m2026-06-13T09:50:57.603568Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 47.62419]
[INFO] [stdout] [2m2026-06-13T09:50:57.603580Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-06-13T09:50:57.603590Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.606013Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 33.11111 at 44100hZ = 1331.8793hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.606102Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1331.8793, 47.62419]
[INFO] [stdout] [2m2026-06-13T09:50:57.606128Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 2
[INFO] [stdout] [2m2026-06-13T09:50:57.606141Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1331.8793
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.606510Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::period_detector[0m[2m:[0m False correlation check...
[INFO] [stdout] [2m2026-06-13T09:50:57.606526Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.606948Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 87.9 at 44100hZ = 501.70648hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.606967Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.606978Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.607603Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 87.9 at 44100hZ = 501.70648hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.607622Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.607634Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.608177Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.610385Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 38.375 at 44100hZ = 1149.1857hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.610405Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (0)
[INFO] [stdout] [2m2026-06-13T09:50:57.610416Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 0.9375
[INFO] [stdout] [2m2026-06-13T09:50:57.610427Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1149.1857, 47.62419]
[INFO] [stdout] [2m2026-06-13T09:50:57.610440Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift detected, reset frames from 0
[INFO] [stdout] [2m2026-06-13T09:50:57.610450Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1149.1857
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.612499Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 38.375 at 44100hZ = 1149.1857hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.612560Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [1331.8793, 1149.1857, 1149.1857]
[INFO] [stdout] [2m2026-06-13T09:50:57.612579Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 0
[INFO] [stdout] [2m2026-06-13T09:50:57.612680Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1149.1857
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.614915Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Period 174.66667 at 44100hZ = 252.48091hZ
[INFO] [stdout] [2m2026-06-13T09:50:57.614976Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Not long enough since shift to check for harmonics (1)
[INFO] [stdout] [2m2026-06-13T09:50:57.615010Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Confident shift at 1
[INFO] [stdout] [2m2026-06-13T09:50:57.615046Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::median[0m[2m:[0m Median filter values: [252.48091, 1149.1857, 1149.1857]
[INFO] [stdout] [2m2026-06-13T09:50:57.615088Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::pitch_detector[0m[2m:[0m Shift not detected, increment frames from 1
[INFO] [stdout] [2m2026-06-13T09:50:57.615119Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Found Frequency: 1149.1857
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.615607Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] [2m2026-06-13T09:50:57.616022Z[0m [34mDEBUG[0m [2mbitstream_autocorrelation::tests[0m[2m:[0m Failed to find frequency
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] test tests::test_from_file ... ok
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_from_files stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_from_files' (19) panicked at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tracing-subscriber-0.3.22/src/fmt/mod.rs:520:14:
[INFO] [stdout] Unable to install global subscriber: SetGlobalDefaultError("a global default trace dispatcher has already been set")
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b6619f77038 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5b6619f77038 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized::<std[d054f6f42beb1baa]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5b6619f77038 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5b6619f77038 - <<std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5b6619f8cb8a - <core[5a1c3e9896636f3a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5b6619f8cb8a - core[5a1c3e9896636f3a]::fmt::write
[INFO] [stdout]    6:     0x5b6619f7bcc2 - std[d054f6f42beb1baa]::io::default_write_fmt::<alloc[154f689e5dd3bae5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5b6619f7bcc2 - <alloc[154f689e5dd3bae5]::vec::Vec<u8> as std[d054f6f42beb1baa]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5b6619f556b6 - <std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5b6619f556b6 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5b6619f6f1a9 - std[d054f6f42beb1baa]::panicking::default_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5b6619dd95ec - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   12:     0x5b6619dd95ec - test[fad20673b750c10e]::test_main_inner::<test[fad20673b750c10e]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5b6619f6f422 - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   14:     0x5b6619f6f422 - std[d054f6f42beb1baa]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5b6619f55772 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5b6619f4d039 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace::<std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5b6619f5648d - __rustc[7ab284efd7f33ea8]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5b6619f8d34c - core[5a1c3e9896636f3a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5b6619f8d0c2 - core[5a1c3e9896636f3a]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1872:5
[INFO] [stdout]   20:     0x5b6619db379b - <core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::boxed::Box<dyn core[5a1c3e9896636f3a]::error::Error + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync>>>::expect
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5b6619d77880 - <tracing_subscriber[23902126074e856e]::fmt::SubscriberBuilder>::init
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tracing-subscriber-0.3.22/src/fmt/mod.rs:520:14
[INFO] [stdout]   22:     0x5b6619d355b6 - bitstream_autocorrelation[12437b6ddd9d4d62]::tests::test_from_files
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:137:14
[INFO] [stdout]   23:     0x5b6619d323d7 - bitstream_autocorrelation[12437b6ddd9d4d62]::tests::test_from_files::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:132:25
[INFO] [stdout]   24:     0x5b6619d49206 - <bitstream_autocorrelation[12437b6ddd9d4d62]::tests::test_from_files::{closure#0} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5b6619dcc6cb - <fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5b6619dcc6cb - test[fad20673b750c10e]::__rust_begin_short_backtrace::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18
[INFO] [stdout]   27:     0x5b6619dd9f45 - test[fad20673b750c10e]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74
[INFO] [stdout]   28:     0x5b6619dd9f45 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x5b6619dd9f45 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5b6619dd9f45 - std[d054f6f42beb1baa]::panicking::catch_unwind::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5b6619dd9f45 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5b6619dd9f45 - test[fad20673b750c10e]::run_test_in_process
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27
[INFO] [stdout]   33:     0x5b6619dd9f45 - test[fad20673b750c10e]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43
[INFO] [stdout]   34:     0x5b6619dd4aa4 - test[fad20673b750c10e]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41
[INFO] [stdout]   35:     0x5b6619dd4aa4 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace::<test[fad20673b750c10e]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5b6619ddcfc2 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x5b6619ddcfc2 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x5b6619ddcfc2 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5b6619ddcfc2 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5b6619ddcfc2 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5b6619ddcfc2 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x5b6619ddcfc2 - <std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5b6619f7695f - <alloc[154f689e5dd3bae5]::boxed::Box<dyn core[5a1c3e9896636f3a]::ops::function::FnOnce<(), Output = ()> + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9
[INFO] [stdout]   44:     0x5b6619f7695f - <std[d054f6f42beb1baa]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7af16a535aa4 - <unknown>
[INFO] [stdout]   46:     0x7af16a5c2a64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_with_microphone stdout ----
[INFO] [stdout] Ok(DeviceDescription { name: "Default Audio Device", manufacturer: None, driver: Some("default"), device_type: Unknown, interface_type: Unknown, direction: Unknown, address: None, extended: ["Default Audio Device"] })
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::test_with_microphone' (20) panicked at src/lib.rs:71:64:
[INFO] [stdout] Failed to get device config.: DeviceNotAvailable
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5b6619f77038 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5b6619f77038 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized::<std[d054f6f42beb1baa]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5b6619f77038 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5b6619f77038 - <<std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5b6619f8cb8a - <core[5a1c3e9896636f3a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5b6619f8cb8a - core[5a1c3e9896636f3a]::fmt::write
[INFO] [stdout]    6:     0x5b6619f7bcc2 - std[d054f6f42beb1baa]::io::default_write_fmt::<alloc[154f689e5dd3bae5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5b6619f7bcc2 - <alloc[154f689e5dd3bae5]::vec::Vec<u8> as std[d054f6f42beb1baa]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5b6619f556b6 - <std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5b6619f556b6 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5b6619f6f1a9 - std[d054f6f42beb1baa]::panicking::default_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5b6619dd95ec - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   12:     0x5b6619dd95ec - test[fad20673b750c10e]::test_main_inner::<test[fad20673b750c10e]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5b6619f6f422 - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   14:     0x5b6619f6f422 - std[d054f6f42beb1baa]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5b6619f55772 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5b6619f4d039 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace::<std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5b6619f5648d - __rustc[7ab284efd7f33ea8]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5b6619f8d34c - core[5a1c3e9896636f3a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5b6619f8d0c2 - core[5a1c3e9896636f3a]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1872:5
[INFO] [stdout]   20:     0x5b6619d227ff - <core[5a1c3e9896636f3a]::result::Result<cpal[da27292389ed56ff]::SupportedStreamConfig, cpal[da27292389ed56ff]::error::DefaultStreamConfigError>>::expect
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5b6619d32817 - bitstream_autocorrelation[12437b6ddd9d4d62]::tests::test_with_microphone::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:71:64
[INFO] [stdout]   22:     0x5b6619d36842 - <core[5a1c3e9896636f3a]::pin::Pin<&mut dyn core[5a1c3e9896636f3a]::future::future::Future<Output = ()>> as core[5a1c3e9896636f3a]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9
[INFO] [stdout]   23:     0x5b6619d8727d - <tokio[1df73f422ff547a6]::runtime::park::CachedParkThread>::block_on::<core[5a1c3e9896636f3a]::pin::Pin<&mut dyn core[5a1c3e9896636f3a]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/park.rs:284:71
[INFO] [stdout]   24:     0x5b6619d84c22 - tokio[1df73f422ff547a6]::task::coop::with_budget::<core[5a1c3e9896636f3a]::task::poll::Poll<()>, <tokio[1df73f422ff547a6]::runtime::park::CachedParkThread>::block_on<core[5a1c3e9896636f3a]::pin::Pin<&mut dyn core[5a1c3e9896636f3a]::future::future::Future<Output = ()>>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:167:5
[INFO] [stdout]   25:     0x5b6619d84c22 - tokio[1df73f422ff547a6]::task::coop::budget::<core[5a1c3e9896636f3a]::task::poll::Poll<()>, <tokio[1df73f422ff547a6]::runtime::park::CachedParkThread>::block_on<core[5a1c3e9896636f3a]::pin::Pin<&mut dyn core[5a1c3e9896636f3a]::future::future::Future<Output = ()>>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:133:5
[INFO] [stdout]   26:     0x5b6619d84c22 - <tokio[1df73f422ff547a6]::runtime::park::CachedParkThread>::block_on::<core[5a1c3e9896636f3a]::pin::Pin<&mut dyn core[5a1c3e9896636f3a]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/park.rs:284:31
[INFO] [stdout]   27:     0x5b6619d56074 - <tokio[1df73f422ff547a6]::runtime::context::blocking::BlockingRegionGuard>::block_on::<core[5a1c3e9896636f3a]::pin::Pin<&mut dyn core[5a1c3e9896636f3a]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/blocking.rs:66:14
[INFO] [stdout]   28:     0x5b6619d74768 - <tokio[1df73f422ff547a6]::runtime::scheduler::multi_thread::MultiThread>::block_on::<core[5a1c3e9896636f3a]::pin::Pin<&mut dyn core[5a1c3e9896636f3a]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/multi_thread/mod.rs:89:22
[INFO] [stdout]   29:     0x5b6619d86e9b - tokio[1df73f422ff547a6]::runtime::context::runtime::enter_runtime::<<tokio[1df73f422ff547a6]::runtime::scheduler::multi_thread::MultiThread>::block_on<core[5a1c3e9896636f3a]::pin::Pin<&mut dyn core[5a1c3e9896636f3a]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   30:     0x5b6619d73e04 - <tokio[1df73f422ff547a6]::runtime::scheduler::multi_thread::MultiThread>::block_on::<core[5a1c3e9896636f3a]::pin::Pin<&mut dyn core[5a1c3e9896636f3a]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/multi_thread/mod.rs:88:9
[INFO] [stdout]   31:     0x5b6619d79864 - <tokio[1df73f422ff547a6]::runtime::runtime::Runtime>::block_on_inner::<core[5a1c3e9896636f3a]::pin::Pin<&mut dyn core[5a1c3e9896636f3a]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:370:50
[INFO] [stdout]   32:     0x5b6619d79a5f - <tokio[1df73f422ff547a6]::runtime::runtime::Runtime>::block_on::<core[5a1c3e9896636f3a]::pin::Pin<&mut dyn core[5a1c3e9896636f3a]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:342:18
[INFO] [stdout]   33:     0x5b6619d35ca3 - bitstream_autocorrelation[12437b6ddd9d4d62]::tests::test_with_microphone
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:120:27
[INFO] [stdout]   34:     0x5b6619d32407 - bitstream_autocorrelation[12437b6ddd9d4d62]::tests::test_with_microphone::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/lib.rs:67:36
[INFO] [stdout]   35:     0x5b6619d49246 - <bitstream_autocorrelation[12437b6ddd9d4d62]::tests::test_with_microphone::{closure#0} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   36:     0x5b6619dcc6cb - <fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   37:     0x5b6619dcc6cb - test[fad20673b750c10e]::__rust_begin_short_backtrace::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18
[INFO] [stdout]   38:     0x5b6619dd9f45 - test[fad20673b750c10e]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74
[INFO] [stdout]   39:     0x5b6619dd9f45 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   40:     0x5b6619dd9f45 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   41:     0x5b6619dd9f45 - std[d054f6f42beb1baa]::panicking::catch_unwind::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   42:     0x5b6619dd9f45 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   43:     0x5b6619dd9f45 - test[fad20673b750c10e]::run_test_in_process
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27
[INFO] [stdout]   44:     0x5b6619dd9f45 - test[fad20673b750c10e]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43
[INFO] [stdout]   45:     0x5b6619dd4aa4 - test[fad20673b750c10e]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41
[INFO] [stdout]   46:     0x5b6619dd4aa4 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace::<test[fad20673b750c10e]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   47:     0x5b6619ddcfc2 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   48:     0x5b6619ddcfc2 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   49:     0x5b6619ddcfc2 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   50:     0x5b6619ddcfc2 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   51:     0x5b6619ddcfc2 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   52:     0x5b6619ddcfc2 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   53:     0x5b6619ddcfc2 - <std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   54:     0x5b6619f7695f - <alloc[154f689e5dd3bae5]::boxed::Box<dyn core[5a1c3e9896636f3a]::ops::function::FnOnce<(), Output = ()> + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9
[INFO] [stdout]   55:     0x5b6619f7695f - <std[d054f6f42beb1baa]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   56:     0x7af16a535aa4 - <unknown>
[INFO] [stdout]   57:     0x7af16a5c2a64 - clone
[INFO] [stdout]   58:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::test_from_files
[INFO] [stdout]     tests::test_with_microphone
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 1 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.21s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "39fb6e9a9a56e6c3d2ea1df9b56e80316d8688b7538996a8cc4595e8c89ed3bb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "39fb6e9a9a56e6c3d2ea1df9b56e80316d8688b7538996a8cc4595e8c89ed3bb", kill_on_drop: false }`
[INFO] [stdout] 39fb6e9a9a56e6c3d2ea1df9b56e80316d8688b7538996a8cc4595e8c89ed3bb
